[INFO] cloning repository https://github.com/javileyes/ExpliCAS
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/javileyes/ExpliCAS" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjavileyes%2FExpliCAS", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjavileyes%2FExpliCAS'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 88ead2235a9748340cb4870e62f9a62b51213fc3
[INFO] testing javileyes/ExpliCAS against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjavileyes%2FExpliCAS" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-6-tc2/source/.cargo/config.toml
[INFO] removed /workspace/builds/worker-6-tc2/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/javileyes/ExpliCAS
[INFO] finished tweaking git repo https://github.com/javileyes/ExpliCAS
[INFO] tweaked toml for git repo https://github.com/javileyes/ExpliCAS written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/javileyes/ExpliCAS on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/javileyes/ExpliCAS already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 59b4789632fbf1617a90e2d4a54ae4bb00a1775b4c199644b70c07611cc5109b
[INFO] running `Command { std: "docker" "start" "-a" "59b4789632fbf1617a90e2d4a54ae4bb00a1775b4c199644b70c07611cc5109b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "59b4789632fbf1617a90e2d4a54ae4bb00a1775b4c199644b70c07611cc5109b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "59b4789632fbf1617a90e2d4a54ae4bb00a1775b4c199644b70c07611cc5109b", kill_on_drop: false }`
[INFO] [stdout] 59b4789632fbf1617a90e2d4a54ae4bb00a1775b4c199644b70c07611cc5109b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9d0da876a47a82e325657627cd3d5de2c3daebaef2b33d0a8ca29232c07c8fce
[INFO] running `Command { std: "docker" "start" "-a" "9d0da876a47a82e325657627cd3d5de2c3daebaef2b33d0a8ca29232c07c8fce", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling smol_str v0.3.6
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling tracing-core v0.1.35
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling anyhow v1.0.100
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling ryu v1.0.20
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling serde_spanned v1.0.3
[INFO] [stderr]    Compiling toml_datetime v0.7.3
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling toml_writer v1.0.4
[INFO] [stderr]    Compiling combine v4.6.7
[INFO] [stderr]    Compiling dirs-sys v0.4.1
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling clap_builder v4.5.53
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling toml_parser v1.0.4
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling fd-lock v3.0.13
[INFO] [stderr]    Compiling toml v0.9.8
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling cas_ast v0.1.0 (/opt/rustwide/workdir/crates/cas_ast)
[INFO] [stderr]    Compiling cas_math v0.1.0 (/opt/rustwide/workdir/crates/cas_math)
[INFO] [stderr]    Compiling cas_formatter v0.1.0 (/opt/rustwide/workdir/crates/cas_formatter)
[INFO] [stderr]    Compiling cas_parser v0.1.0 (/opt/rustwide/workdir/crates/cas_parser)
[INFO] [stderr]    Compiling tracing v0.1.43
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling jni-sys v0.3.0
[INFO] [stderr]    Compiling cesu8 v1.1.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling jni v0.21.1
[INFO] [stderr]    Compiling rustyline v12.0.0
[INFO] [stderr]    Compiling clap v4.5.53
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling cas_api_models v0.1.0 (/opt/rustwide/workdir/crates/cas_api_models)
[INFO] [stderr]    Compiling dirs v5.0.1
[INFO] [stderr]    Compiling cas_session_core v0.1.0 (/opt/rustwide/workdir/crates/cas_session_core)
[INFO] [stderr]    Compiling cas_solver_core v0.1.0 (/opt/rustwide/workdir/crates/cas_solver_core)
[INFO] [stderr]    Compiling cas_engine v0.1.0 (/opt/rustwide/workdir/crates/cas_engine)
[INFO] [stderr]    Compiling cas_solver v0.1.0 (/opt/rustwide/workdir/crates/cas_solver)
[INFO] [stderr]    Compiling cas_session v0.1.0 (/opt/rustwide/workdir/crates/cas_session)
[INFO] [stderr]    Compiling cas_didactic v0.1.0 (/opt/rustwide/workdir/crates/cas_didactic)
[INFO] [stderr]    Compiling cas_android_ffi v0.1.0 (/opt/rustwide/workdir/crates/cas_android_ffi)
[INFO] [stderr]    Compiling cas_cli v0.1.0 (/opt/rustwide/workdir/crates/cas_cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized] target(s) in 49.75s
[INFO] running `Command { std: "docker" "inspect" "9d0da876a47a82e325657627cd3d5de2c3daebaef2b33d0a8ca29232c07c8fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9d0da876a47a82e325657627cd3d5de2c3daebaef2b33d0a8ca29232c07c8fce", kill_on_drop: false }`
[INFO] [stdout] 9d0da876a47a82e325657627cd3d5de2c3daebaef2b33d0a8ca29232c07c8fce
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8cd124831b5e965d25a3e57206be48c206ec51214cbae6faab0df8a91db7fc07
[INFO] running `Command { std: "docker" "start" "-a" "8cd124831b5e965d25a3e57206be48c206ec51214cbae6faab0df8a91db7fc07", kill_on_drop: false }`
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling zerocopy v0.8.30
[INFO] [stderr]    Compiling zerocopy-derive v0.8.30
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling cas_api_models v0.1.0 (/opt/rustwide/workdir/crates/cas_api_models)
[INFO] [stderr]    Compiling criterion-plot v0.6.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling cas_session_core v0.1.0 (/opt/rustwide/workdir/crates/cas_session_core)
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling predicates-core v1.0.9
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling cas_math v0.1.0 (/opt/rustwide/workdir/crates/cas_math)
[INFO] [stderr]    Compiling assert_cmd v2.1.1
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling predicates-tree v1.0.12
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling insta v1.46.0
[INFO] [stderr]    Compiling cas_ast v0.1.0 (/opt/rustwide/workdir/crates/cas_ast)
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.9.0
[INFO] [stderr]    Compiling criterion v0.7.0
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling cas_solver_core v0.1.0 (/opt/rustwide/workdir/crates/cas_solver_core)
[INFO] [stderr]    Compiling cas_formatter v0.1.0 (/opt/rustwide/workdir/crates/cas_formatter)
[INFO] [stderr]    Compiling cas_parser v0.1.0 (/opt/rustwide/workdir/crates/cas_parser)
[INFO] [stderr]    Compiling cas_engine v0.1.0 (/opt/rustwide/workdir/crates/cas_engine)
[INFO] [stderr]    Compiling cas_solver v0.1.0 (/opt/rustwide/workdir/crates/cas_solver)
[INFO] [stderr]    Compiling cas_session v0.1.0 (/opt/rustwide/workdir/crates/cas_session)
[INFO] [stderr]    Compiling cas_didactic v0.1.0 (/opt/rustwide/workdir/crates/cas_didactic)
[INFO] [stderr]    Compiling cas_android_ffi v0.1.0 (/opt/rustwide/workdir/crates/cas_android_ffi)
[INFO] [stderr]    Compiling cas_cli v0.1.0 (/opt/rustwide/workdir/crates/cas_cli)
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 1m 19s
[INFO] running `Command { std: "docker" "inspect" "8cd124831b5e965d25a3e57206be48c206ec51214cbae6faab0df8a91db7fc07", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8cd124831b5e965d25a3e57206be48c206ec51214cbae6faab0df8a91db7fc07", kill_on_drop: false }`
[INFO] [stdout] 8cd124831b5e965d25a3e57206be48c206ec51214cbae6faab0df8a91db7fc07
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6ede548a3f96cce8817a252be2dd5f192b42530d5cc8d92b420d5620ff6d4240
[INFO] running `Command { std: "docker" "start" "-a" "6ede548a3f96cce8817a252be2dd5f192b42530d5cc8d92b420d5620ff6d4240", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 0.35s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cas_android_ffi-47c763f7f66b11e0)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test tests::test_eval_invalid_opts ... ok
[INFO] [stdout] test tests::test_eval_parse_error ... ok
[INFO] [stdout] test tests::test_no_hold_leak ... ok
[INFO] [stdout] test tests::test_steps_mode ... ok
[INFO] [stdout] test tests::test_eval_success ... ok
[INFO] [stdout] test tests::test_opts_defaults ... ok
[INFO] [stdout] test tests::test_opts_custom ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cas_api_models-f78e9dc3e59b90f2)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test wire_types::tests::domain_wire_from_mode_sets_mode ... ok
[INFO] [stdout] test wire_types::tests::engine_wire_error_from_eval_runtime_error_maps_stateful_hint ... ok
[INFO] [stdout] test wire::tests::build_eval_wire_reply_adds_expected_sections ... ok
[INFO] [stdout] test wire::tests::build_eval_wire_reply_omits_steps_when_disabled ... ok
[INFO] [stdout] test wire_types::tests::engine_wire_response_invalid_options_json_has_expected_contract ... ok
[INFO] [stdout] test wire_types::tests::engine_wire_error_from_eval_runtime_error_maps_internal_error ... ok
[INFO] [stdout] test wire_types::tests::engine_wire_error_session_ref_not_supported_has_hint ... ok
[INFO] [stdout] test wire_types::tests::error_wire_output_from_eval_error_message_maps_parse_errors ... ok
[INFO] [stdout] test wire_types::tests::engine_wire_error_invalid_options_json_sets_contract_fields ... ok
[INFO] [stdout] test wire_types::tests::eval_run_options_requested_pretty_detects_true_literal ... ok
[INFO] [stdout] test wire_types::tests::eval_wire_output_from_build_sets_schema_and_budget_mode ... ok
[INFO] [stdout] test wire_types::tests::limit_wire_response_parse_error_has_code_contract ... ok
[INFO] [stdout] test wire_types::tests::limit_wire_response_ok_omits_error_and_code ... ok
[INFO] [stdout] test wire_types::tests::options_wire_from_eval_axes_sets_all_fields ... ok
[INFO] [stdout] test wire_types::tests::parse_eval_special_command_parses_solve_and_limit ... ok
[INFO] [stdout] test wire_types::tests::parse_eval_special_command_rejects_invalid_forms ... ok
[INFO] [stdout] test wire_types::tests::semantics_wire_from_eval_axes_sets_all_fields ... ok
[INFO] [stdout] test wire_types::tests::substitute_run_options_from_mode_flags_sets_fields ... ok
[INFO] [stdout] test wire_types::tests::substitute_run_options_parse_optional_json_fast_paths_common_shapes ... ok
[INFO] [stdout] test wire_types::tests::substitute_run_options_parse_optional_json_uses_defaults_on_invalid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cas_ast-a12af00361320a27)
[INFO] [stdout] 
[INFO] [stdout] running 60 tests
[INFO] [stdout] test builtin::tests::test_builtin_ids_cache ... ok
[INFO] [stdout] test builtin::tests::test_builtin_ids_lookup_non_identity_fallback ... ok
[INFO] [stdout] test builtin::tests::test_builtin_count ... ok
[INFO] [stdout] test builtin::tests::test_all_iterator ... ok
[INFO] [stdout] test builtin::tests::test_builtin_names ... ok
[INFO] [stdout] test eq::tests::test_eq_name ... ok
[INFO] [stdout] test eq::tests::test_is_eq_name ... ok
[INFO] [stdout] test builtin::tests::test_builtin_ids_initialized_identity ... ok
[INFO] [stdout] test eq::tests::test_wrap_unwrap_eq ... ok
[INFO] [stdout] test eq::tests::test_non_eq_returns_none ... ok
[INFO] [stdout] test expression::tests::test_binary_add_fast_path_keeps_positive_first ... ok
[INFO] [stdout] test expr_path::tests::test_path_to_string ... ok
[INFO] [stdout] test expression::tests::test_binary_add_fast_path_preserves_canonical_order ... ok
[INFO] [stdout] test expr_path::tests::test_is_prefix ... ok
[INFO] [stdout] test expression::tests::test_canonicity_preserved_with_commutativity_guards ... ok
[INFO] [stdout] test expression::tests::test_context_new_preloads_builtin_identity_layout ... ok
[INFO] [stdout] test expression::tests::test_mul_commutativity_function_with_matrix ... ok
[INFO] [stdout] test expression::tests::test_mul_commutativity_matrix ... ok
[INFO] [stdout] test expression::tests::test_mul_commutativity_mixed ... ok
[INFO] [stdout] test expression::tests::test_mul_commutativity_scalar ... ok
[INFO] [stdout] test hold::tests::test_is_hold ... ok
[INFO] [stdout] test hold::tests::test_strip_all_holds_nested ... ok
[INFO] [stdout] test hold::tests::test_strip_no_change_when_no_holds ... ok
[INFO] [stdout] test hold::tests::test_unwrap_hold ... ok
[INFO] [stdout] test hold::tests::test_wrap_unwrap_roundtrip ... ok
[INFO] [stdout] test span::tests::test_span_basic ... ok
[INFO] [stdout] test span::tests::test_span_display ... ok
[INFO] [stdout] test span::tests::test_span_empty ... ok
[INFO] [stdout] test symbol::tests::test_builtin_ids_are_logical_prefix ... ok
[INFO] [stdout] test symbol::tests::test_different_symbols ... ok
[INFO] [stdout] test symbol::tests::test_get_id_existing ... ok
[INFO] [stdout] test symbol::tests::test_get_id_missing ... ok
[INFO] [stdout] test symbol::tests::test_intern_deduplication ... ok
[INFO] [stdout] test symbol::tests::test_intern_roundtrip ... ok
[INFO] [stdout] test symbol::tests::test_len_counts_builtin_prefix ... ok
[INFO] [stdout] test symbol::tests::test_unicode_symbols ... ok
[INFO] [stdout] test traversal::tests::test_collect_variables_basic ... ok
[INFO] [stdout] test traversal::tests::test_collect_variables_constant_only ... ok
[INFO] [stdout] test traversal::tests::test_collect_variables_no_duplicates ... ok
[INFO] [stdout] test traversal::tests::test_count_all_nodes_nested ... ok
[INFO] [stdout] test traversal::tests::test_count_all_nodes_simple ... ok
[INFO] [stdout] test traversal::tests::test_count_nodes_and_max_depth ... ok
[INFO] [stdout] test traversal::tests::test_count_nodes_matching_div ... ok
[INFO] [stdout] test traversal::tests::test_deep_tree_no_stack_overflow ... ok
[INFO] [stdout] test views::surd_tests::test_square_free_decompose ... ok
[INFO] [stdout] test views::surd_tests::test_surd_sum_view_basic ... ok
[INFO] [stdout] test views::surd_tests::test_surd_sum_view_div_exponent_form ... ok
[INFO] [stdout] test views::surd_tests::test_surd_sum_view_rejects_variable ... ok
[INFO] [stdout] test views::surd_tests::test_surd_sum_view_sqrt_function ... ok
[INFO] [stdout] test views::surd_tests::test_surd_sum_view_square_free_normalization ... ok
[INFO] [stdout] test views::tests::test_mul_builder_basic ... ok
[INFO] [stdout] test views::tests::test_mul_builder_compresses_exponents ... ok
[INFO] [stdout] test views::tests::test_build_as_div ... ok
[INFO] [stdout] test views::tests::test_mul_builder_idempotent ... ok
[INFO] [stdout] test views::tests::test_mul_with_div ... ok
[INFO] [stdout] test views::tests::test_rational_fn_view_pow_neg1 ... ok
[INFO] [stdout] test views::tests::test_rational_fn_view_preserves_structure ... ok
[INFO] [stdout] test views::tests::test_reciprocal_pow ... ok
[INFO] [stdout] test views::tests::test_simple_fraction ... ok
[INFO] [stdout] test views::tests::test_rational_fn_view_div ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/context_stats_nodes_created.rs (/opt/rustwide/target/debug/deps/context_stats_nodes_created-2aaa23924c1e0bbd)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test nodes_created_consistent_between_add_and_add_raw ... ok
[INFO] [stdout] test nodes_created_does_not_increment_on_dedup ... ok
[INFO] [stdout] test nodes_created_increments_on_new_var ... ok
[INFO] [stdout] test nodes_created_increments_on_new_expression ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cas_cli-ad93a3f05fb0c9b1)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test repl::help_command::tests::parse_help_command_input_with_topic_reads_topic ... ok
[INFO] [stdout] test repl::help_command::tests::parse_help_command_input_without_topic_is_general ... ok
[INFO] [stdout] test repl::help_topics::tests::help_topic_text_returns_known_topic ... ok
[INFO] [stdout] test repl::general_help::tests::general_help_text_contains_core_sections ... ok
[INFO] [stdout] test repl::panic_guard::tests::generate_short_error_id_returns_six_hex_chars ... ok
[INFO] [stdout] test repl::help_topics::tests::help_topic_text_returns_none_for_unknown_topic ... ok
[INFO] [stdout] test repl::panic_guard::tests::panic_payload_to_message_reads_str_payload ... ok
[INFO] [stdout] test repl::panic_guard::tests::panic_payload_to_message_reads_string_payload ... ok
[INFO] [stdout] test repl::panic_guard::tests::panic_report_and_user_messages_include_error_id ... ok
[INFO] [stdout] test repl::wire::tests::test_open_file_converts_to_info ... ok
[INFO] [stdout] test repl::wire::tests::test_data_not_serialized_when_none ... ok
[INFO] [stdout] test repl::wire::tests::test_repl_msg_to_wire_msg ... ok
[INFO] [stdout] test repl::wire::tests::test_repl_reply_to_wire_reply ... ok
[INFO] [stdout] test repl::wire::tests::test_round_trip_serialization ... ok
[INFO] [stdout] test repl::wire::tests::test_wire_msg_with_data_serialization ... ok
[INFO] [stdout] test repl::wire::tests::test_wire_msg_with_span_and_data ... ok
[INFO] [stdout] test repl::wire::tests::test_wire_msg_with_span_serialization ... ok
[INFO] [stdout] test repl::wire::tests::test_wire_msg_serialization ... ok
[INFO] [stdout] test repl::wire::tests::test_wire_reply_serialization ... ok
[INFO] [stdout] test repl::wire::tests::test_write_file_converts_to_info ... ok
[INFO] [stdout] test repl::core_tests::tests::test_core_set_steps_off_returns_ui_delta ... ok
[INFO] [stdout] test repl::core_tests::tests::test_core_help_returns_output ... ok
[INFO] [stdout] test repl::commands_system::tests::evaluate_linear_system_command_message_accepts_space_form ... ok
[INFO] [stdout] test repl::commands_system::tests::evaluate_linear_system_command_message_accepts_parenthesized_form ... ok
[INFO] [stdout] test repl::core_tests::tests::test_core_set_verbose_returns_ui_delta ... ok
[INFO] [stdout] test repl::core_tests::tests::test_core_eval_simple_arithmetic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/advanced_simplification.rs (/opt/rustwide/target/debug/deps/advanced_simplification-cf294d4627aa3737)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test engine_tests::test_logarithmic_mirror_engine ... ok
[INFO] [stdout] test engine_tests::test_triple_angle_engine ... ok
[INFO] [stdout] test engine_tests::test_ramanujan_shadow_engine ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/asin_acos_negation_tests.rs (/opt/rustwide/target/debug/deps/asin_acos_negation_tests-22cd566f0f6c1f6d)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_arcsin_arccos_positive_basic ... ok
[INFO] [stdout] test test_asin_acos_both_pairs ... ok
[INFO] [stdout] test test_arcsin_arccos_negated_basic ... ok
[INFO] [stdout] test test_asin_acos_mixed_signs_no_match ... ok
[INFO] [stdout] test test_asin_acos_cancellation ... ok
[INFO] [stdout] test test_asin_acos_generalization_consistency ... ok
[INFO] [stdout] test test_asin_acos_negated_basic ... ok
[INFO] [stdout] test test_asin_acos_positive_basic ... ok
[INFO] [stdout] test test_asin_acos_negated_with_variable ... ok
[INFO] [stdout] test test_asin_acos_negated_scattered ... ok
[INFO] [stdout] test test_asin_acos_with_extra_terms ... ok
[INFO] [stdout] test test_asin_acos_nary_positive ... ok
[INFO] [stdout] test test_asin_acos_nary_negated ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/branch_mode_tests.rs (/opt/rustwide/target/debug/deps/branch_mode_tests-05dc096c78f69c4f)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_principal_arctan_tan_pi_evaluates_correctly ... ok
[INFO] [stdout] test test_strict_arccos_cos_x_unchanged ... ok
[INFO] [stdout] test test_principal_arccos_cos_x_simplifies ... ok
[INFO] [stdout] test test_principal_arctan_tan_y_with_warning ... ok
[INFO] [stdout] test test_principal_arctan_tan_x_simplifies ... ok
[INFO] [stdout] test test_principal_arcsin_sin_x_simplifies ... ok
[INFO] [stdout] test test_both_modes_tan_arctan_x ... ok
[INFO] [stdout] test test_both_modes_sin_arcsin_x ... ok
[INFO] [stdout] test test_strict_arctan_tan_x_unchanged ... ok
[INFO] [stdout] test test_strict_arcsin_sin_x_unchanged ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/canonical_tests.rs (/opt/rustwide/target/debug/deps/canonical_tests-eb3d4f7034b57f97)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_associativity_mul ... ok
[INFO] [stdout] test test_associativity_add ... ok
[INFO] [stdout] test test_metamorphic_add_zero ... ok
[INFO] [stdout] test test_commutativity_mul ... ok
[INFO] [stdout] test test_commutativity_add ... ok
[INFO] [stdout] test test_n0_neg_number_normalized ... ok
[INFO] [stdout] test test_associativity_nested_add ... ok
[INFO] [stdout] test test_metamorphic_double_neg ... ok
[INFO] [stdout] test test_metamorphic_mul_one ... ok
[INFO] [stdout] test test_metamorphic_div_one ... ok
[INFO] [stdout] test test_metamorphic_pow_one ... ok
[INFO] [stdout] test test_structural_invariants ... ok
[INFO] [stdout] test test_idempotence_complex ... ok
[INFO] [stdout] test test_n0_structural_invariant_with_negatives ... ok
[INFO] [stdout] test test_idempotence_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cli_contract_tests.rs (/opt/rustwide/target/debug/deps/cli_contract_tests-7f3663ff29be0747)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_eval_rejects_legacy_cli_budget_alias ... ok
[INFO] [stdout] test test_eval_help_shows_budget_options ... ok
[INFO] [stdout] test test_help_shows_correct_commands ... ok
[INFO] [stdout] test test_eval_text_format ... ok
[INFO] [stdout] test test_eval_budget_exceeded_best_effort ... ok
[INFO] [stdout] test test_eval_budget_exceeded_strict ... ok
[INFO] [stdout] test test_eval_emits_wire_output ... ok
[INFO] [stdout] test test_eval_with_budget_preset ... ok
[INFO] [stdout] test test_eval_wire_output_has_schema_version ... ok
[INFO] [stdout] test test_eval_strict_mode ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cli_wire_contract_tests.rs (/opt/rustwide/target/debug/deps/cli_wire_contract_tests-1233d55e3f8bcfdf)
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test test_envelope_wire_assume_log_exp_surfaces_warning_and_guard ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_generic_vs_assume_even_power_and_abs_split ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_generic_vs_assume_log_exp_split ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_result_eval ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_strict_generic_assume_abs_radical_split ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_strict_vs_generic_exp_ln_x_split ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_strict_x_over_x_surfaces_blocked_hints ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_transparency_preserves_domain_requirements ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_transparency_requires ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_v1_structure ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_value_domain_gates_explicit_i_family ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_value_domain_gates_imaginary_warning ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_envelope_wire_value_domain_log_exp_split_and_constant_stability ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_error_code_starts_with_e ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_error_kind_in_known_set ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_no_hold_in_error ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_no_hold_in_result ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_parse_error_has_kind_code ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_schema_version_is_1 ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_success ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_eval_wire_success_has_budget ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_ffi_mock_domain_requirements_are_preserved ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] test test_ffi_mock_required_conditions_schema ... ignored, Uses cargo run internally, causing lock contention in CI
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 23 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/complex_integration_tests.rs (/opt/rustwide/target/debug/deps/complex_integration_tests-f992e9e9394c9cab)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_nested_logs_exponents ... ok
[INFO] [stdout] test test_trig_algebra_solver ... ok
[INFO] [stdout] test test_complex_solver_distribution ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/debug_inequality.rs (/opt/rustwide/target/debug/deps/debug_inequality-9eb16dd9650029f6)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_rational_inequality_1_over_x ... ok
[INFO] [stdout] test test_linear_equation_with_fractions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/debug_pi_canon.rs (/opt/rustwide/target/debug/deps/debug_pi_canon-f7f5dc69e132cbd2)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test debug_pi_forms ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/debug_sec_tan.rs (/opt/rustwide/target/debug/deps/debug_sec_tan-dc2c4deb8606c45b)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] [2m2026-03-27T12:11:03.726847Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Sub(ExprId(1610612742), ExprId(7))
[INFO] [stdout] [2m2026-03-27T12:11:03.728462Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mCore [3mbudget[0m[2m=[0m8
[INFO] [stdout] [2m2026-03-27T12:11:03.728463Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mCore [3mbudget[0m[2m=[0m8
[INFO] [stdout] [2m2026-03-27T12:11:03.728823Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Sub(ExprId(1610612742), ExprId(7))
[INFO] [stdout] [2m2026-03-27T12:11:03.729048Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Sub(ExprId(1610612739), ExprId(1610612741))
[INFO] [stdout] [2m2026-03-27T12:11:03.729763Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Pow(ExprId(2147483649), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.729774Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Sub(ExprId(1610612739), ExprId(1610612741))
[INFO] [stdout] [2m2026-03-27T12:11:03.729797Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Function(3, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.729812Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.729964Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Sub(ExprId(1610612739), ExprId(1610612741))
[INFO] [stdout] [2m2026-03-27T12:11:03.730330Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483649), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.730412Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483649), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.730436Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(3, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.730482Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(3, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.730644Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.730687Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.731027Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.731291Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m     [DEBUG] Global Rule 'Secant to Reciprocal Cosine' applied: ExprId(2147483649) -> ExprId(1610612745)
[INFO] [stdout] [2m2026-03-27T12:11:03.731394Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483652), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.731533Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m       [DEBUG] Global Rule 'Secant to Reciprocal Cosine' applied: ExprId(2147483649) -> ExprId(1610612746)
[INFO] [stdout] [2m2026-03-27T12:11:03.731488Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(2, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.731655Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.731825Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m       [DEBUG] Rule 'Tan to Sin/Cos' applied: ExprId(2147483652) -> ExprId(1610612747)
[INFO] [stdout] [2m2026-03-27T12:11:03.731826Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Div(ExprId(7), ExprId(2147483656))
[INFO] [stdout] [2m2026-03-27T12:11:03.732006Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.731879Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Div(ExprId(7), ExprId(2147483657))
[INFO] [stdout] [2m2026-03-27T12:11:03.732071Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.731972Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Div(ExprId(2147483657), ExprId(2147483658))
[INFO] [stdout] [2m2026-03-27T12:11:03.732167Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(0, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.732136Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.732342Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m           [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.732596Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.732609Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.732616Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m           [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.732670Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.732683Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m           [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.732960Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.733534Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.733696Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.733888Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.734271Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m     [DEBUG] Global Rule 'Power of a Quotient' applied: ExprId(1610612747) -> ExprId(1610612752)
[INFO] [stdout] [2m2026-03-27T12:11:03.734308Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Div(ExprId(1610612750), ExprId(1610612751))
[INFO] [stdout] [2m2026-03-27T12:11:03.734350Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Pow(ExprId(7), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.734371Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.734384Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.734852Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Sub(ExprId(1610612749), ExprId(7))
[INFO] [stdout] [2m2026-03-27T12:11:03.734858Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m   [DEBUG] Global Rule 'Power of a Quotient' applied: ExprId(1610612746) -> ExprId(1610612750)
[INFO] [stdout] [2m2026-03-27T12:11:03.734931Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m       [DEBUG] Global Rule 'Evaluate Numeric Power' applied: ExprId(1610612750) -> ExprId(7)
[INFO] [stdout] [2m2026-03-27T12:11:03.735202Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Div(ExprId(1610612748), ExprId(1610612749))
[INFO] [stdout] [2m2026-03-27T12:11:03.735227Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(7), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.735227Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735250Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735265Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735341Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m     [DEBUG] Global Rule 'Evaluate Numeric Power' applied: ExprId(1610612748) -> ExprId(7)
[INFO] [stdout] [2m2026-03-27T12:11:03.735366Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735368Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Pow(ExprId(2147483657), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.735383Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483656), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.735395Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.735402Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.735407Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735413Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735452Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Sub(ExprId(1610612739), ExprId(1610612748))
[INFO] [stdout] [2m2026-03-27T12:11:03.735730Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Pow(ExprId(2147483652), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.735759Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Function(2, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.735772Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.735914Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.735843Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483649), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.735990Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(3, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.736006Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.736102Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m [DEBUG] Global Rule 'Canonicalize Negation' applied: ExprId(1610612753) -> ExprId(1610612755)
[INFO] [stdout] [2m2026-03-27T12:11:03.736128Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Add(ExprId(1610612752), ExprId(1073741842))
[INFO] [stdout] [2m2026-03-27T12:11:03.736250Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Div(ExprId(7), ExprId(1610612749))
[INFO] [stdout] [2m2026-03-27T12:11:03.736269Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.736276Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483652), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.736283Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483656), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.736334Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.736426Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Function(2, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.736444Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.736455Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Neg(ExprId(1610612741))
[INFO] [stdout] [2m2026-03-27T12:11:03.736473Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(2147483652), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.736631Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Pow(ExprId(1610612747), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.736779Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Div(ExprId(2147483657), ExprId(2147483658))
[INFO] [stdout] [2m2026-03-27T12:11:03.736856Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(0, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.736918Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m           [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.737135Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.737059Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m         [DEBUG] Visiting: Function(1, [ExprId(536870912)])
[INFO] [stdout] [2m2026-03-27T12:11:03.737346Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m           [DEBUG] Visiting: Variable(43)
[INFO] [stdout] [2m2026-03-27T12:11:03.737720Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 2, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.737973Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m   [DEBUG] Global Rule 'Canonicalize Negation' applied: ExprId(1610612756) -> ExprId(1610612759)
[INFO] [stdout] [2m2026-03-27T12:11:03.738050Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Add(ExprId(1610612755), ExprId(1073741846))
[INFO] [stdout] [2m2026-03-27T12:11:03.738379Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m [DEBUG] Global Rule 'Secant-Tangent Pythagorean Identity' applied: ExprId(1610612755) -> ExprId(7)
[INFO] [stdout] [2m2026-03-27T12:11:03.738395Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Div(ExprId(7), ExprId(1610612751))
[INFO] [stdout] [2m2026-03-27T12:11:03.738524Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.738664Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.738688Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.738707Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Pow(ExprId(2147483657), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.738615Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.739282Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mCore [3miters[0m[2m=[0m2 [3mrewrites[0m[2m=[0m5
[INFO] [stdout] [2m2026-03-27T12:11:03.739462Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m     [DEBUG] Visiting: Neg(ExprId(1610612741))
[INFO] [stderr]      Running tests/debug_test_47.rs (/opt/rustwide/target/debug/deps/debug_test_47-c6195ce2f155de9e)
[INFO] [stdout] [2m2026-03-27T12:11:03.739654Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m       [DEBUG] Visiting: Pow(ExprId(2147483652), ExprId(2))
[INFO] [stdout] [2m2026-03-27T12:11:03.739421Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mCore [3miters[0m[2m=[0m2 [3mrewrites[0m[2m=[0m5 [3mchanged[0m[2m=[0mtrue
[INFO] [stdout] [2m2026-03-27T12:11:03.740306Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mTransform [3mbudget[0m[2m=[0m6
[INFO] [stdout] [2m2026-03-27T12:11:03.740424Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] test debug_sec_tan_limited ... ok
[INFO] [stdout] [2m2026-03-27T12:11:03.740316Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m   [DEBUG] Global Rule 'Secant-Tangent Pythagorean Identity' applied: ExprId(1610612759) -> ExprId(7)
[INFO] [stdout] [2m2026-03-27T12:11:03.740633Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.740660Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m   [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.740727Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform::rule_application[0m[2m:[0m [DEBUG] Global Rule 'Subtraction Self-Cancel' applied: ExprId(1610612761) -> ExprId(26)
[INFO] [stdout] [2m2026-03-27T12:11:03.740743Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 0, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.740988Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 0, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.741135Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mCore [3miters[0m[2m=[0m2 [3mrewrites[0m[2m=[0m6
[INFO] [stdout] [2m2026-03-27T12:11:03.741194Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mCore [3miters[0m[2m=[0m2 [3mrewrites[0m[2m=[0m6 [3mchanged[0m[2m=[0mtrue
[INFO] [stdout] [2m2026-03-27T12:11:03.741209Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mTransform [3mbudget[0m[2m=[0m6
[INFO] [stdout] [2m2026-03-27T12:11:03.741226Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 0, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.741377Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mTransform [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0
[INFO] [stdout] [2m2026-03-27T12:11:03.741460Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mTransform [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0 [3mchanged[0m[2m=[0mfalse
[INFO] [stdout] [2m2026-03-27T12:11:03.741618Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mPostCleanup [3mbudget[0m[2m=[0m4
[INFO] [stdout] [2m2026-03-27T12:11:03.741672Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 0, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.741802Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mPostCleanup [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0
[INFO] [stdout] [2m2026-03-27T12:11:03.741876Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mPostCleanup [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0 [3mchanged[0m[2m=[0mfalse
[INFO] [stdout] [2m2026-03-27T12:11:03.741296Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mTransform [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0
[INFO] [stdout] [2m2026-03-27T12:11:03.741942Z[0m [32m INFO[0m [2msimplify[0m[2m:[0m pipeline_complete [3mcore_iters[0m[2m=[0m2 [3mtransform_iters[0m[2m=[0m1 [3mrationalize_iters[0m[2m=[0m0 [3mpost_iters[0m[2m=[0m1 [3mtotal_rewrites[0m[2m=[0m6
[INFO] [stdout] [2m2026-03-27T12:11:03.741951Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mTransform [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0 [3mchanged[0m[2m=[0mfalse
[INFO] [stdout] [2m2026-03-27T12:11:03.742036Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_start [3mphase[0m[2m=[0mPostCleanup [3mbudget[0m[2m=[0m4
[INFO] [stdout] [2m2026-03-27T12:11:03.742059Z[0m [34mDEBUG[0m [2mcas_engine::engine::transform[0m[2m:[0m [DEBUG] Visiting: Number(Ratio { numer: 1, denom: 1 })
[INFO] [stdout] [2m2026-03-27T12:11:03.742171Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_fixed_point [3mphase[0m[2m=[0mPostCleanup [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0
[INFO] [stdout] [2m2026-03-27T12:11:03.742198Z[0m [34mDEBUG[0m [2msimplify[0m[2m:[0m phase_end [3mphase[0m[2m=[0mPostCleanup [3miters[0m[2m=[0m1 [3mrewrites[0m[2m=[0m0 [3mchanged[0m[2m=[0mfalse
[INFO] [stdout] [2m2026-03-27T12:11:03.742213Z[0m [32m INFO[0m [2msimplify[0m[2m:[0m pipeline_complete [3mcore_iters[0m[2m=[0m2 [3mtransform_iters[0m[2m=[0m1 [3mrationalize_iters[0m[2m=[0m0 [3mpost_iters[0m[2m=[0m1 [3mtotal_rewrites[0m[2m=[0m5
[INFO] [stdout] test debug_sec_tan_pythagorean ... ok
[INFO] [stdout] test debug_sec_tan_without_minus_one ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test debug_test_47 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/debug_undefined.rs (/opt/rustwide/target/debug/deps/debug_undefined-e3d52bd29607eb7d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_rational_inequality_undefined_debug ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/determinism_tests.rs (/opt/rustwide/target/debug/deps/determinism_tests-ae4097f69ba1ef54)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_determinism_repl_accumulated_state ... ok
[INFO] [stdout] test test_determinism_simplify_mixed ... ok
[INFO] [stdout] test test_determinism_rationalize_explicit ... ok
[INFO] [stdout] test test_determinism_rationalize_200x ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.54s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/domain_cli_contract_tests.rs (/opt/rustwide/target/debug/deps/domain_cli_contract_tests-6d5e3490f18fcd02)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test cli_domain_strict_x_div_x_stays_unchanged ... ok
[INFO] [stdout] test cli_domain_strict_partial_cancel_contract ... ok
[INFO] [stdout] test cli_domain_default_is_generic ... ok
[INFO] [stdout] test cli_domain_assume_emits_warning ... ok
[INFO] [stdout] test cli_wire_includes_domain_mode ... ok
[INFO] [stdout] test cli_domain_generic_x_div_x_simplifies_to_1 ... ok
[INFO] [stdout] test cli_domain_strict_numeric_preserves_fraction_in_auto_eval ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/equivalence_tests.rs (/opt/rustwide/target/debug/deps/equivalence_tests-f1b708b74c79278c)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_associativity_equivalence ... ok
[INFO] [stdout] test test_exponent_equivalence ... ok
[INFO] [stdout] test test_deep_associativity ... ok
[INFO] [stdout] test test_mixed_distributive_associativity ... ok
[INFO] [stdout] test test_log_exp_equivalence ... ok
[INFO] [stdout] test test_not_equivalent ... ok
[INFO] [stdout] test test_commutativity_equivalence ... ok
[INFO] [stdout] test test_polynomial_equivalence ... ok
[INFO] [stdout] test test_complex_equivalence ... ok
[INFO] [stdout] test test_zero_property_equivalence ... ok
[INFO] [stdout] test test_numeric_verification ... ok
[INFO] [stdout] test test_trig_identity_equivalence ... ok
[INFO] [stdout] test test_trig_associativity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/gcd_torture_tests.rs (/opt/rustwide/target/debug/deps/gcd_torture_tests-4a5f990353318b52)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_gcd_42_coprime ... ok
[INFO] [stdout] test test_gcd_45_fraction_reduction ... ok
[INFO] [stdout] test test_gcd_41_non_monic ... ok
[INFO] [stdout] test test_gcd_44_coefficient_swell ... ok
[INFO] [stdout] test test_gcd_43_high_degree_sparse ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/generalized_negation_tests.rs (/opt/rustwide/target/debug/deps/generalized_negation_tests-f420169acfd50255)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test test_generalized_atan_positive_basic ... ok
[INFO] [stdout] test test_generalized_atan_mixed_signs_no_match ... ok
[INFO] [stdout] test test_generalized_atan_positive_and_negative_pairs ... ok
[INFO] [stdout] test test_generalized_complex_cancellation ... ok
[INFO] [stdout] test test_generalized_atan_negative_basic ... ok
[INFO] [stdout] test test_generalized_alternating_pairs ... ok
[INFO] [stdout] test test_generalized_double_negation ... ok
[INFO] [stdout] test test_generalized_deeply_nested_negation ... ok
[INFO] [stdout] test test_generalized_expression_consistency ... ok
[INFO] [stdout] test test_generalized_negative_pair_cancels_with_positive_pi ... ok
[INFO] [stdout] test test_generalized_atan_positive_with_terms ... ok
[INFO] [stdout] test test_generalized_atan_negative_with_terms ... ok
[INFO] [stdout] test test_generalized_many_pairs ... ok
[INFO] [stdout] test test_generalized_negative_pair_with_multiplication ... ok
[INFO] [stdout] test test_generalized_positive_pair_cancels_with_negative_pi ... ok
[INFO] [stdout] test test_generalized_readme_example ... ok
[INFO] [stdout] test test_generalized_negative_pair_with_addition ... ok
[INFO] [stdout] test test_generalized_single_negated_atan ... ok
[INFO] [stdout] test test_generalized_original_sympy_beating_case ... ok
[INFO] [stdout] test test_generalized_two_positive_pairs ... ok
[INFO] [stdout] test test_generalized_two_negative_pairs ... ok
[INFO] [stdout] test test_generalized_three_atans_one_negative_pair ... ok
[INFO] [stdout] test test_generalized_nary_all_negative_terms ... ok
[INFO] [stdout] test test_generalized_nary_with_negatives ... ok
[INFO] [stdout] test test_generalized_scattered_negative_pair ... ok
[INFO] [stdout] test test_generalized_many_terms_with_negative_pair ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/hyperbolic_tests.rs (/opt/rustwide/target/debug/deps/hyperbolic_tests-a9393a2b46c098fe)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test test_atanh_zero ... ok
[INFO] [stdout] test test_asinh_zero ... ok
[INFO] [stdout] test test_acosh_cosh ... ok
[INFO] [stdout] test test_acosh_one ... ok
[INFO] [stdout] test test_asinh_sinh ... ok
[INFO] [stdout] test test_atanh_tanh ... ok
[INFO] [stdout] test test_atanh_negative ... ok
[INFO] [stdout] test test_asinh_negative ... ok
[INFO] [stdout] test test_cosh_acosh ... ok
[INFO] [stdout] test test_double_composition ... ok
[INFO] [stdout] test test_composition_identity_chain ... ok
[INFO] [stdout] test test_hyperbolic_pythagorean ... ok
[INFO] [stdout] test test_cosh_zero ... ok
[INFO] [stdout] test test_cosh_negative ... ok
[INFO] [stdout] test test_composition_with_negative ... ok
[INFO] [stdout] test test_hyperbolic_pythagorean_reverse ... ok
[INFO] [stdout] test test_mixed_hyperbolic ... ok
[INFO] [stdout] test test_nested_hyperbolic ... ok
[INFO] [stdout] test test_sinh_asinh ... ok
[INFO] [stdout] test test_multiple_compositions ... ok
[INFO] [stdout] test test_hyperbolic_with_negatives ... ok
[INFO] [stdout] test test_sinh_zero ... ok
[INFO] [stdout] test test_pythagorean_with_variable ... ok
[INFO] [stdout] test test_sinh_negative ... ok
[INFO] [stdout] test test_tanh_atanh ... ok
[INFO] [stdout] test test_tanh_negative ... ok
[INFO] [stdout] test test_tanh_zero ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/idempotence_tests.rs (/opt/rustwide/target/debug/deps/idempotence_tests-d1b09a8e1f5516cf)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_level1_does_not_apply_to_multisurd ... ok
[INFO] [stdout] test test_idempotence_single_surd_denominator ... ok
[INFO] [stdout] test test_idempotence_multisurd_denominator ... ok
[INFO] [stdout] test test_idempotence_binomial_surd_denominator ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/inequality_tests.rs (/opt/rustwide/target/debug/deps/inequality_tests-9e12bab316bcca1f)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_inequality_flip_negative_coeff ... ok
[INFO] [stdout] test test_abs_inequality_complex ... ok
[INFO] [stdout] test test_inequality_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-78f0a37aea513f12)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_end_to_end_simplification ... ok
[INFO] [stdout] test test_nested_simplification ... ok
[INFO] [stdout] test test_integration_command ... ok
[INFO] [stdout] test test_exponent_simplification ... ok
[INFO] [stdout] test test_root_simplification ... ok
[INFO] [stdout] test test_polynomial_factorization_integration ... ok
[INFO] [stdout] test test_logarithm_simplification ... ok
[INFO] [stdout] test test_polynomial_simplification ... ok
[INFO] [stdout] test test_fraction_simplification ... ok
[INFO] [stdout] test test_enhanced_integration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/inverse_relations_tests.rs (/opt/rustwide/target/debug/deps/inverse_relations_tests-858ae52eafa41b01)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test test_arccos_unchanged ... ok
[INFO] [stdout] test test_acsc_abbreviation ... ok
[INFO] [stdout] test test_arccot_to_arctan ... ok
[INFO] [stdout] test test_arccsc_to_arcsin ... ok
[INFO] [stdout] test test_arccot_symbolic ... ok
[INFO] [stdout] test test_acot_abbreviation ... ok
[INFO] [stdout] test test_arccsc_symbolic ... ok
[INFO] [stdout] test test_54_arcsec_arccos_relation ... ok
[INFO] [stdout] test test_arctan_unchanged ... ok
[INFO] [stdout] test test_arcsin_unchanged ... ok
[INFO] [stdout] test test_arcsec_to_arccos ... ok
[INFO] [stdout] test test_arcsec_symbolic ... ok
[INFO] [stdout] test test_tan_arccot ... ok
[INFO] [stdout] test test_arcsec_in_expression ... ok
[INFO] [stdout] test test_sin_arcsec ... ok
[INFO] [stdout] test test_asec_abbreviation ... ok
[INFO] [stdout] test test_cos_arccsc ... ok
[INFO] [stdout] test test_multiple_conversions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/inverse_trig_tests.rs (/opt/rustwide/target/debug/deps/inverse_trig_tests-96651c90df6a7192)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test test_arccos_one ... ok
[INFO] [stdout] test test_arcsin_negative ... ok
[INFO] [stdout] test test_arccos_zero ... ok
[INFO] [stdout] test test_arccos_arcsin_sum ... ok
[INFO] [stdout] test test_arcsin_arccos_sum ... ok
[INFO] [stdout] test test_arccos_cos_composition ... ok
[INFO] [stdout] test test_arccos_negative ... ok
[INFO] [stdout] test test_arcsin_one ... ok
[INFO] [stdout] test test_arcsin_arccos_with_expression ... ok
[INFO] [stdout] test test_arctan_reciprocal_sum ... ok
[INFO] [stdout] test test_arcsin_sin_composition ... ok
[INFO] [stdout] test test_arcsin_zero ... ok
[INFO] [stdout] test test_arctan_tan_composition ... ok
[INFO] [stdout] test test_arctan_reciprocal_sum_reverse ... ok
[INFO] [stdout] test test_arctan_negative ... ok
[INFO] [stdout] test test_arctan_zero ... ok
[INFO] [stdout] test test_arctan_one ... ok
[INFO] [stdout] test test_cos_arccos_composition ... ok
[INFO] [stdout] test test_composition_identity_chain ... ok
[INFO] [stdout] test test_double_composition ... ok
[INFO] [stdout] test test_arctan_with_polynomial ... ok
[INFO] [stdout] test test_nested_inverse_trig ... ok
[INFO] [stdout] test test_composition_with_negative ... ok
[INFO] [stdout] test test_multiple_compositions ... ok
[INFO] [stdout] test test_sin_arcsin_composition ... ok
[INFO] [stdout] test test_inverse_trig_with_arithmetic ... ok
[INFO] [stdout] test test_tan_arctan_composition ... ok
[INFO] [stdout] test test_mixed_trig_and_inverse ... ok
[INFO] [stdout] test test_sum_with_negatives ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/inverse_trig_torture_tests.rs (/opt/rustwide/target/debug/deps/inverse_trig_torture_tests-f5b3503f1d99db59)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_48_atan_reciprocal_sign_symbolic ... ok
[INFO] [stdout] test test_47_complementary_identity_symbolic ... ok
[INFO] [stdout] test test_atan_inverse_positive_t_numeric ... ok
[INFO] [stdout] test test_tan_atan_roundtrip_numeric ... ok
[INFO] [stdout] test test_46_principal_values_numeric ... ok
[INFO] [stdout] test test_49_machin_formula_numeric ... ok
[INFO] [stdout] test test_50_tan_asin_composition_symbolic ... ok
[INFO] [stdout] test test_cos_asin_composition_numeric ... ok
[INFO] [stdout] test test_sin_acos_composition_numeric ... ok
[INFO] [stdout] test test_sin_atan_composition_numeric ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/limit_contract_tests.rs (/opt/rustwide/target/debug/deps/limit_contract_tests-f0f36454db7baa38)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_limit_rational_poly_json ... FAILED
[INFO] [stdout] test test_limit_neg_infinity_parity ... FAILED
[INFO] [stdout] test test_limit_higher_num_degree_infinity ... FAILED
[INFO] [stdout] test test_limit_deg_num_less_than_deg_den ... FAILED
[INFO] [stdout] test test_limit_residual_with_warning_json ... FAILED
[INFO] [stdout] test test_limit_x_to_infinity_text ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_rational_poly_json stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_rational_poly_json' (423) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stdout]   14:     0x62773ccd13d1 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_rational_poly_json
[INFO] [stdout]   15:     0x62773ccd0453 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_rational_poly_json::{closure#0}
[INFO] [stdout]   16:     0x62773ccd7f06 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_rational_poly_json::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_neg_infinity_parity stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_neg_infinity_parity' (422) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stdout]   14:     0x62773ccd179e - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_neg_infinity_parity
[INFO] [stdout]   15:     0x62773ccd04b3 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_neg_infinity_parity::{closure#0}
[INFO] [stdout]   16:     0x62773ccd7f86 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_neg_infinity_parity::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_higher_num_degree_infinity stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_higher_num_degree_infinity' (421) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stdout]   14:     0x62773ccd1b01 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_higher_num_degree_infinity
[INFO] [stdout]   15:     0x62773ccd0513 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_higher_num_degree_infinity::{closure#0}
[INFO] [stdout]   16:     0x62773ccd8006 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_higher_num_degree_infinity::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_deg_num_less_than_deg_den stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_deg_num_less_than_deg_den' (420) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stdout]   14:     0x62773ccd194e - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_deg_num_less_than_deg_den
[INFO] [stdout]   15:     0x62773ccd04e3 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_deg_num_less_than_deg_den::{closure#0}
[INFO] [stdout]   16:     0x62773ccd7fc6 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_deg_num_less_than_deg_den::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_residual_with_warning_json stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_residual_with_warning_json' (424) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stdout]   14:     0x62773ccd1d31 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_residual_with_warning_json
[INFO] [stdout]   15:     0x62773ccd0543 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_residual_with_warning_json::{closure#0}
[INFO] [stdout]   16:     0x62773ccd8046 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_residual_with_warning_json::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_limit_x_to_infinity_text stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_limit_x_to_infinity_text' (428) panicked at crates/cas_cli/tests/limit_contract_tests.rs:39:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/cas_cli": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62773cd4ebfa - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x62773cd6288a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    2:     0x62773cd53482 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x62773cd2dabf - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x62773cd471b9 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]    5:     0x62773cce401c - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x62773cd47372 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x62773cd2db78 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x62773cd25519 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x62773cd2e88d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]   10:     0x62773cd62f7c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x62773ccd05ed - limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}
[INFO] [stdout]   12:     0x62773ccd4770 - <core[a96a4c5c53f902a3]::result::Result<std[ec4e911328de40a6]::process::Output, std[ec4e911328de40a6]::io::error::Error>>::unwrap_or_else::<limit_contract_tests[d8dbc6a78ec5b980]::run_limit::{closure#0}>
[INFO] [stdout]   13:     0x62773ccd11e2 - limit_contract_tests[d8dbc6a78ec5b980]::run_limit
[INFO] [stderr] error: test failed, to rerun pass `-p cas_cli --test limit_contract_tests`
[INFO] [stdout]   14:     0x62773ccd15f8 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_x_to_infinity_text
[INFO] [stdout]   15:     0x62773ccd0483 - limit_contract_tests[d8dbc6a78ec5b980]::test_limit_x_to_infinity_text::{closure#0}
[INFO] [stdout]   16:     0x62773ccd7f46 - <limit_contract_tests[d8dbc6a78ec5b980]::test_limit_x_to_infinity_text::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x62773ccd80fb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]   18:     0x62773cce4aeb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]   19:     0x62773cce0204 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x62773cce76f2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x62773cd4e50f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x7c373ce4aaa4 - <unknown>
[INFO] [stdout]   23:     0x7c373ced7a64 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_limit_deg_num_less_than_deg_den
[INFO] [stdout]     test_limit_higher_num_degree_infinity
[INFO] [stdout]     test_limit_neg_infinity_parity
[INFO] [stdout]     test_limit_rational_poly_json
[INFO] [stdout]     test_limit_residual_with_warning_json
[INFO] [stdout]     test_limit_x_to_infinity_text
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6ede548a3f96cce8817a252be2dd5f192b42530d5cc8d92b420d5620ff6d4240", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6ede548a3f96cce8817a252be2dd5f192b42530d5cc8d92b420d5620ff6d4240", kill_on_drop: false }`
[INFO] [stdout] 6ede548a3f96cce8817a252be2dd5f192b42530d5cc8d92b420d5620ff6d4240
